Dec 03 17:39:42.915 INFO testing build-plan-0.1.1 against master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61 for beta-1.31-5
Dec 03 17:39:42.916 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-0/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 03 17:39:43.114 INFO [stdout] f4a89cc6e6ae3dedd1491a8d2e91b649bb77a3a2a16c9a0922b9f88817d8458b
Dec 03 17:39:43.116 INFO running `"docker" "start" "-a" "f4a89cc6e6ae3dedd1491a8d2e91b649bb77a3a2a16c9a0922b9f88817d8458b"`
Dec 03 17:39:43.494 INFO [stderr] usermod: no changes
Dec 03 17:39:43.551 INFO [stderr]    Compiling build-plan v0.1.1 (/source)
Dec 03 17:39:44.813 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.30s
Dec 03 17:39:44.816 INFO [stderr] su: No module specific data is present
Dec 03 17:39:45.225 INFO running `"docker" "inspect" "f4a89cc6e6ae3dedd1491a8d2e91b649bb77a3a2a16c9a0922b9f88817d8458b"`
Dec 03 17:39:45.293 INFO running `"docker" "rm" "-f" "f4a89cc6e6ae3dedd1491a8d2e91b649bb77a3a2a16c9a0922b9f88817d8458b"`
Dec 03 17:39:45.379 INFO [stdout] f4a89cc6e6ae3dedd1491a8d2e91b649bb77a3a2a16c9a0922b9f88817d8458b
Dec 03 17:39:45.381 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-0/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 03 17:39:45.548 INFO [stdout] 66ba442f668a0ec93a2ab2dc619218c2c6c1ed7ddef01cbb189f92cc42e2781e
Dec 03 17:39:45.550 INFO running `"docker" "start" "-a" "66ba442f668a0ec93a2ab2dc619218c2c6c1ed7ddef01cbb189f92cc42e2781e"`
Dec 03 17:39:45.852 INFO [stderr] usermod: no changes
Dec 03 17:39:45.900 INFO [stderr]    Compiling build-plan v0.1.1 (/source)
Dec 03 17:39:50.017 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.14s
Dec 03 17:39:50.022 INFO [stderr] su: No module specific data is present
Dec 03 17:39:50.265 INFO running `"docker" "inspect" "66ba442f668a0ec93a2ab2dc619218c2c6c1ed7ddef01cbb189f92cc42e2781e"`
Dec 03 17:39:50.349 INFO running `"docker" "rm" "-f" "66ba442f668a0ec93a2ab2dc619218c2c6c1ed7ddef01cbb189f92cc42e2781e"`
Dec 03 17:39:50.424 INFO [stdout] 66ba442f668a0ec93a2ab2dc619218c2c6c1ed7ddef01cbb189f92cc42e2781e
Dec 03 17:39:50.428 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-0/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/beta-1.31-5/master#8940af3cea4a9a9deabcaf843b2f8cad9a83fc61:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +8940af3cea4a9a9deabcaf843b2f8cad9a83fc61-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 03 17:39:50.644 INFO [stdout] 07e62b73f64e6611d5dec5d06f4a96235576292e6db657cb721299ef9058361a
Dec 03 17:39:50.646 INFO running `"docker" "start" "-a" "07e62b73f64e6611d5dec5d06f4a96235576292e6db657cb721299ef9058361a"`
Dec 03 17:39:51.140 INFO [stderr] usermod: no changes
Dec 03 17:39:51.194 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.03s
Dec 03 17:39:51.195 INFO [stderr]      Running /target/debug/deps/build_plan-2cbcb8e138bfdf10
Dec 03 17:39:51.197 INFO [stdout] 
Dec 03 17:39:51.197 INFO [stdout] running 0 tests
Dec 03 17:39:51.197 INFO [stdout] 
Dec 03 17:39:51.197 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 17:39:51.197 INFO [stdout] 
Dec 03 17:39:51.197 INFO [stderr]      Running /target/debug/deps/integration-d6a11019645bc3b2
Dec 03 17:39:51.200 INFO [stdout] 
Dec 03 17:39:51.200 INFO [stdout] running 1 test
Dec 03 17:39:51.241 INFO [stdout] test reflect ... FAILED
Dec 03 17:39:51.241 INFO [stdout] 
Dec 03 17:39:51.241 INFO [stdout] failures:
Dec 03 17:39:51.241 INFO [stdout] 
Dec 03 17:39:51.241 INFO [stdout] ---- reflect stdout ----
Dec 03 17:39:51.241 INFO [stdout] thread 'reflect' panicked at 'called `Result::unwrap()` on an `Err` value: Error("EOF while parsing a value", line: 1, column: 0)', libcore/result.rs:1009:5
Dec 03 17:39:51.241 INFO [stdout] stack backtrace:
Dec 03 17:39:51.241 INFO [stdout]    0:     0x565082b271df - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h3a8b83e1922cbdde
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Dec 03 17:39:51.241 INFO [stdout]    1:     0x565082b339e7 - std::sys_common::backtrace::print::h00d3155a29b4020f
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/sys_common/backtrace.rs:71
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/sys_common/backtrace.rs:59
Dec 03 17:39:51.241 INFO [stdout]    2:     0x565082b2c59f - std::panicking::default_hook::{{closure}}::hd7465c742e79e1bb
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/panicking.rs:211
Dec 03 17:39:51.241 INFO [stdout]    3:     0x565082b2c29e - std::panicking::default_hook::h9e3966f2aa2a6e12
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/panicking.rs:221
Dec 03 17:39:51.241 INFO [stdout]    4:     0x565082b2cc7e - std::panicking::rust_panic_with_hook::h587f091ae747d080
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/panicking.rs:476
Dec 03 17:39:51.241 INFO [stdout]    5:     0x565082b2c821 - std::panicking::continue_panic_fmt::hb3a4fdede87f43a8
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/panicking.rs:390
Dec 03 17:39:51.241 INFO [stdout]    6:     0x565082b2c705 - rust_begin_unwind
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/panicking.rs:325
Dec 03 17:39:51.241 INFO [stdout]    7:     0x565082b71fec - core::panicking::panic_fmt::h6f9cebf5e7474a0b
Dec 03 17:39:51.241 INFO [stdout]                                at libcore/panicking.rs:77
Dec 03 17:39:51.241 INFO [stdout]    8:     0x565082aa5170 - core::result::unwrap_failed::hc89bb02162448f62
Dec 03 17:39:51.241 INFO [stdout]                                at libcore/macros.rs:26
Dec 03 17:39:51.241 INFO [stdout]    9:     0x565082aa374f - <core::result::Result<T, E>>::unwrap::h2ec7cd7604ab298b
Dec 03 17:39:51.241 INFO [stdout]                                at libcore/result.rs:808
Dec 03 17:39:51.241 INFO [stdout]   10:     0x565082aa835e - integration::reflect::h9c2346979597f857
Dec 03 17:39:51.241 INFO [stdout]                                at tests/integration.rs:18
Dec 03 17:39:51.241 INFO [stdout]   11:     0x565082aa8179 - integration::reflect::{{closure}}::h9f37f06300004ded
Dec 03 17:39:51.241 INFO [stdout]                                at tests/integration.rs:9
Dec 03 17:39:51.241 INFO [stdout]   12:     0x565082a803dd - core::ops::function::FnOnce::call_once::h2cdbc611e2db6faf
Dec 03 17:39:51.241 INFO [stdout]                                at libcore/ops/function.rs:238
Dec 03 17:39:51.241 INFO [stdout]   13:     0x565082aaa70e - <F as alloc::boxed::FnBox<A>>::call_box::hac903f91577a156c
Dec 03 17:39:51.241 INFO [stdout]                                at libtest/lib.rs:1468
Dec 03 17:39:51.241 INFO [stdout]                                at libcore/ops/function.rs:238
Dec 03 17:39:51.241 INFO [stdout]                                at liballoc/boxed.rs:672
Dec 03 17:39:51.241 INFO [stdout]   14:     0x565082b3e999 - __rust_maybe_catch_panic
Dec 03 17:39:51.241 INFO [stdout]                                at libpanic_unwind/lib.rs:102
Dec 03 17:39:51.241 INFO [stdout]   15:     0x565082acc362 - std::sys_common::backtrace::__rust_begin_short_backtrace::hb8f0d0309526c184
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/panicking.rs:289
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/panic.rs:392
Dec 03 17:39:51.241 INFO [stdout]                                at libtest/lib.rs:1423
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/sys_common/backtrace.rs:136
Dec 03 17:39:51.241 INFO [stdout]   16:     0x565082acce14 - std::panicking::try::do_call::hc2f7c8b9a348d8db
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/thread/mod.rs:409
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/panic.rs:313
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/panicking.rs:310
Dec 03 17:39:51.241 INFO [stdout]   17:     0x565082b3e999 - __rust_maybe_catch_panic
Dec 03 17:39:51.241 INFO [stdout]                                at libpanic_unwind/lib.rs:102
Dec 03 17:39:51.241 INFO [stdout]   18:     0x565082aba04c - <F as alloc::boxed::FnBox<A>>::call_box::h6bfded618e480b32
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/panicking.rs:289
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/panic.rs:392
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/thread/mod.rs:408
Dec 03 17:39:51.241 INFO [stdout]                                at liballoc/boxed.rs:672
Dec 03 17:39:51.241 INFO [stdout]   19:     0x565082b2962d - std::sys_common::thread::start_thread::h4c28257d67cdf9cb
Dec 03 17:39:51.241 INFO [stdout]                                at liballoc/boxed.rs:682
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/sys_common/thread.rs:24
Dec 03 17:39:51.241 INFO [stdout]   20:     0x565082b1c385 - std::sys::unix::thread::Thread::new::thread_start::hfecb2e7eff8fd34f
Dec 03 17:39:51.241 INFO [stdout]                                at libstd/sys/unix/thread.rs:90
Dec 03 17:39:51.241 INFO [stdout]   21:     0x7f1da28666b9 - start_thread
Dec 03 17:39:51.241 INFO [stdout]   22:     0x7f1da238641c - clone
Dec 03 17:39:51.241 INFO [stdout]   23:                0x0 - <unknown>
Dec 03 17:39:51.241 INFO [stdout] 
Dec 03 17:39:51.241 INFO [stdout] 
Dec 03 17:39:51.241 INFO [stdout] failures:
Dec 03 17:39:51.241 INFO [stdout]     reflect
Dec 03 17:39:51.241 INFO [stdout] 
Dec 03 17:39:51.241 INFO [stdout] test result: FAILED. 0 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Dec 03 17:39:51.242 INFO [stdout] 
Dec 03 17:39:51.242 INFO [stderr] error: test failed, to rerun pass '--test integration'
Dec 03 17:39:51.244 INFO [stderr] su: No module specific data is present
Dec 03 17:39:51.546 INFO running `"docker" "inspect" "07e62b73f64e6611d5dec5d06f4a96235576292e6db657cb721299ef9058361a"`
Dec 03 17:39:51.609 INFO running `"docker" "rm" "-f" "07e62b73f64e6611d5dec5d06f4a96235576292e6db657cb721299ef9058361a"`
Dec 03 17:39:51.682 INFO [stdout] 07e62b73f64e6611d5dec5d06f4a96235576292e6db657cb721299ef9058361a
